[INFO] cloning repository https://github.com/michaelkirk/yocalhost
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/michaelkirk/yocalhost" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmichaelkirk%2Fyocalhost", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmichaelkirk%2Fyocalhost'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 5c06540bfe6f99ef853188e1249b228eaac8defe
[INFO] testing michaelkirk/yocalhost against master#2fe50cd72c476ebacdedb14893e9632b4de961c2 for pr-116088-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmichaelkirk%2Fyocalhost" "/workspace/builds/worker-6-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/michaelkirk/yocalhost on toolchain 2fe50cd72c476ebacdedb14893e9632b4de961c2
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/michaelkirk/yocalhost
[INFO] finished tweaking git repo https://github.com/michaelkirk/yocalhost
[INFO] tweaked toml for git repo https://github.com/michaelkirk/yocalhost written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/michaelkirk/yocalhost already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded windows-targets v0.48.5
[INFO] [stderr]   Downloaded anstyle-wincon v3.0.1
[INFO] [stderr]   Downloaded equivalent v1.0.1
[INFO] [stderr]   Downloaded windows-targets v0.52.0
[INFO] [stderr]   Downloaded tokio-util v0.7.10
[INFO] [stderr]   Downloaded mio v0.8.9
[INFO] [stderr]   Downloaded futures v0.3.29
[INFO] [stderr]   Downloaded itoa v1.0.9
[INFO] [stderr]   Downloaded windows_i686_msvc v0.48.5
[INFO] [stderr]   Downloaded unicode-bidi v0.3.13
[INFO] [stderr]   Downloaded futures-macro v0.3.29
[INFO] [stderr]   Downloaded http-body v0.4.5
[INFO] [stderr]   Downloaded getrandom v0.2.11
[INFO] [stderr]   Downloaded hashbrown v0.14.3
[INFO] [stderr]   Downloaded regex v1.10.2
[INFO] [stderr]   Downloaded windows_aarch64_gnullvm v0.52.0
[INFO] [stderr]   Downloaded regex-automata v0.4.3
[INFO] [stderr]   Downloaded windows_i686_gnu v0.52.0
[INFO] [stderr]   Downloaded windows-sys v0.52.0
[INFO] [stderr]   Downloaded windows-sys v0.48.0
[INFO] [stderr]   Downloaded windows_i686_msvc v0.52.0
[INFO] [stderr]   Downloaded windows_aarch64_msvc v0.52.0
[INFO] [stderr]   Downloaded windows_x86_64_gnu v0.52.0
[INFO] [stderr]   Downloaded zerocopy-derive v0.7.28
[INFO] [stderr]   Downloaded windows_i686_gnu v0.48.5
[INFO] [stderr]   Downloaded windows_x86_64_gnu v0.48.5
[INFO] [stderr]   Downloaded windows_x86_64_msvc v0.48.5
[INFO] [stderr]   Downloaded libc v0.2.150
[INFO] [stderr]   Downloaded windows_x86_64_msvc v0.52.0
[INFO] [stderr]   Downloaded windows_aarch64_msvc v0.48.5
[INFO] [stderr]   Downloaded windows_x86_64_gnullvm v0.52.0
[INFO] [stderr]   Downloaded regex-syntax v0.8.2
[INFO] [stderr]   Downloaded windows_aarch64_gnullvm v0.48.5
[INFO] [stderr]   Downloaded windows_x86_64_gnullvm v0.48.5
[INFO] [stderr]   Downloaded tokio v1.34.0
[INFO] [stderr]   Downloaded rustix v0.38.26
[INFO] [stderr]   Downloaded gimli v0.28.1
[INFO] [stderr]   Downloaded futures-util v0.3.29
[INFO] [stderr]   Downloaded hyper v0.14.27
[INFO] [stderr]   Downloaded syn v2.0.39
[INFO] [stderr]   Downloaded clap_builder v4.4.9
[INFO] [stderr]   Downloaded aho-corasick v1.1.2
[INFO] [stderr]   Downloaded h2 v0.3.22
[INFO] [stderr]   Downloaded zerocopy v0.7.28
[INFO] [stderr]   Downloaded addr2line v0.21.0
[INFO] [stderr]   Downloaded rustc-demangle v0.1.23
[INFO] [stderr]   Downloaded futures-executor v0.3.29
[INFO] [stderr]   Downloaded clap v4.4.10
[INFO] [stderr]   Downloaded socket2 v0.4.10
[INFO] [stderr]   Downloaded futures-task v0.3.29
[INFO] [stderr]   Downloaded parking_lot_core v0.9.9
[INFO] [stderr]   Downloaded backtrace v0.3.69
[INFO] [stderr]   Downloaded async-speed-limit v0.4.1
[INFO] [stderr]   Downloaded anstyle-parse v0.2.2
[INFO] [stderr]   Downloaded anstream v0.6.4
[INFO] [stderr]   Downloaded clap_lex v0.6.0
[INFO] [stderr]   Downloaded clap_derive v4.4.7
[INFO] [stderr]   Downloaded hyper-staticfile v0.9.5
[INFO] [stderr]   Downloaded ahash v0.8.6
[INFO] [stderr]   Downloaded termcolor v1.4.0
[INFO] [stderr]   Downloaded humantime v2.1.0
[INFO] [stderr]   Downloaded lock_api v0.4.11
[INFO] [stderr]   Downloaded serde_derive v1.0.193
[INFO] [stderr]   Downloaded winapi-util v0.1.6
[INFO] [stderr]   Downloaded httpdate v1.0.3
[INFO] [stderr]   Downloaded try-lock v0.2.4
[INFO] [stderr]   Downloaded signal-hook-registry v1.4.1
[INFO] [stderr]   Downloaded futures-sink v0.3.29
[INFO] [stderr]   Downloaded futures-core v0.3.29
[INFO] [stderr]   Downloaded redox_syscall v0.4.1
[INFO] [stderr]   Downloaded is-terminal v0.4.9
[INFO] [stderr]   Downloaded parking_lot v0.12.1
[INFO] [stderr]   Downloaded futures-channel v0.3.29
[INFO] [stderr]   Downloaded scopeguard v1.2.0
[INFO] [stderr]   Downloaded env_logger v0.10.1
[INFO] [stderr]   Downloaded indexmap v2.1.0
[INFO] [stderr]   Downloaded http-range v0.1.5
[INFO] [stderr]   Downloaded futures-io v0.3.29
[INFO] [stderr]   Downloaded once_cell v1.18.0
[INFO] [stderr]   Downloaded socket2 v0.5.5
[INFO] [stderr]   Downloaded hermit-abi v0.3.3
[INFO] [stderr]   Downloaded allocator-api2 v0.2.16
[INFO] [stderr]   Downloaded object v0.32.1
[INFO] [stderr]   Downloaded smallvec v1.11.2
[INFO] [stderr]   Downloaded proc-macro2 v1.0.70
[INFO] [stderr]   Downloaded tokio-macros v2.2.0
[INFO] [stderr]   Downloaded futures-timer v3.0.2
[INFO] [stderr]   Downloaded utf8-width v0.1.7
[INFO] [stderr]   Downloaded byte-unit v4.0.19
[INFO] [stderr]   Downloaded anstyle-query v1.0.0
[INFO] [stderr]   Downloaded colorchoice v1.0.0
[INFO] [stderr]   Downloaded utf8parse v0.2.1
[INFO] [stderr]   Downloaded anstyle v1.0.4
[INFO] [stderr]   Downloaded heck v0.4.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3934ab86dcf89b519ae02b793b6aef0abe8ecf1d2ff558ce11b7c8f29130b5ad
[INFO] running `Command { std: "docker" "start" "-a" "3934ab86dcf89b519ae02b793b6aef0abe8ecf1d2ff558ce11b7c8f29130b5ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3934ab86dcf89b519ae02b793b6aef0abe8ecf1d2ff558ce11b7c8f29130b5ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3934ab86dcf89b519ae02b793b6aef0abe8ecf1d2ff558ce11b7c8f29130b5ad", kill_on_drop: false }`
[INFO] [stdout] 3934ab86dcf89b519ae02b793b6aef0abe8ecf1d2ff558ce11b7c8f29130b5ad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 78261d6f765e1e7403dbe07a74f16d832badd1186388f8ac78dd0ac030603440
[INFO] running `Command { std: "docker" "start" "-a" "78261d6f765e1e7403dbe07a74f16d832badd1186388f8ac78dd0ac030603440", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.150
[INFO] [stderr]    Compiling proc-macro2 v1.0.70
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling memchr v2.6.4
[INFO] [stderr]    Compiling futures-core v0.3.29
[INFO] [stderr]    Compiling pin-project-lite v0.2.13
[INFO] [stderr]    Compiling futures-task v0.3.29
[INFO] [stderr]    Compiling parking_lot_core v0.9.9
[INFO] [stderr]    Compiling futures-channel v0.3.29
[INFO] [stderr]    Compiling smallvec v1.11.2
[INFO] [stderr]    Compiling bytes v1.5.0
[INFO] [stderr]    Compiling futures-sink v0.3.29
[INFO] [stderr]    Compiling futures-util v0.3.29
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling lock_api v0.4.11
[INFO] [stderr]    Compiling futures-io v0.3.29
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling itoa v1.0.9
[INFO] [stderr]    Compiling quote v1.0.33
[INFO] [stderr]    Compiling unicase v2.7.0
[INFO] [stderr]    Compiling syn v2.0.39
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling tinyvec v1.6.0
[INFO] [stderr]    Compiling http v0.2.11
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling socket2 v0.5.5
[INFO] [stderr]    Compiling mio v0.8.9
[INFO] [stderr]    Compiling signal-hook-registry v1.4.1
[INFO] [stderr]    Compiling parking_lot v0.12.1
[INFO] [stderr]    Compiling num_cpus v1.16.0
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling getrandom v0.2.11
[INFO] [stderr]    Compiling rustix v0.38.26
[INFO] [stderr]    Compiling hashbrown v0.14.3
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling httparse v1.8.0
[INFO] [stderr]    Compiling mime_guess v2.0.4
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling unicode-normalization v0.1.22
[INFO] [stderr]    Compiling anstyle-parse v0.2.2
[INFO] [stderr]    Compiling aho-corasick v1.1.2
[INFO] [stderr]    Compiling anstyle v1.0.4
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling regex-syntax v0.8.2
[INFO] [stderr]    Compiling try-lock v0.2.4
[INFO] [stderr]    Compiling unicode-bidi v0.3.13
[INFO] [stderr]    Compiling serde v1.0.193
[INFO] [stderr]    Compiling indexmap v2.1.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling bitflags v2.4.1
[INFO] [stderr]    Compiling percent-encoding v2.3.1
[INFO] [stderr]    Compiling linux-raw-sys v0.4.12
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling anstream v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling form_urlencoded v1.2.1
[INFO] [stderr]    Compiling idna v0.5.0
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling http-body v0.4.5
[INFO] [stderr]    Compiling regex-automata v0.4.3
[INFO] [stderr]    Compiling socket2 v0.4.10
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling mime v0.3.17
[INFO] [stderr]    Compiling clap_lex v0.6.0
[INFO] [stderr]    Compiling tower-service v0.3.2
[INFO] [stderr]    Compiling is-terminal v0.4.9
[INFO] [stderr]    Compiling url v2.5.0
[INFO] [stderr]    Compiling clap_builder v4.4.9
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling http-range v0.1.5
[INFO] [stderr]    Compiling log v0.4.20
[INFO] [stderr]    Compiling futures-macro v0.3.29
[INFO] [stderr]    Compiling tokio-macros v2.2.0
[INFO] [stderr]    Compiling clap_derive v4.4.7
[INFO] [stderr]    Compiling futures-timer v3.0.2
[INFO] [stderr]    Compiling regex v1.10.2
[INFO] [stderr]    Compiling termcolor v1.4.0
[INFO] [stderr]    Compiling tokio v1.34.0
[INFO] [stderr]    Compiling utf8-width v0.1.7
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling env_logger v0.10.1
[INFO] [stderr]    Compiling byte-unit v4.0.19
[INFO] [stderr]    Compiling clap v4.4.10
[INFO] [stderr]    Compiling futures-executor v0.3.29
[INFO] [stderr]    Compiling futures v0.3.29
[INFO] [stderr]    Compiling tokio-util v0.7.10
[INFO] [stderr]    Compiling async-speed-limit v0.4.1
[INFO] [stderr]    Compiling h2 v0.3.22
[INFO] [stderr]    Compiling hyper v0.14.27
[INFO] [stderr]    Compiling hyper-staticfile v0.9.5
[INFO] [stderr]    Compiling yocalhost v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 12s
[INFO] running `Command { std: "docker" "inspect" "78261d6f765e1e7403dbe07a74f16d832badd1186388f8ac78dd0ac030603440", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78261d6f765e1e7403dbe07a74f16d832badd1186388f8ac78dd0ac030603440", kill_on_drop: false }`
[INFO] [stdout] 78261d6f765e1e7403dbe07a74f16d832badd1186388f8ac78dd0ac030603440
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 112ca2a64762bfdce596e5ee89e1df4cd742a3db7525e79ec22c732b10afab64
[INFO] running `Command { std: "docker" "start" "-a" "112ca2a64762bfdce596e5ee89e1df4cd742a3db7525e79ec22c732b10afab64", kill_on_drop: false }`
[INFO] [stderr]    Compiling yocalhost v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.34s
[INFO] running `Command { std: "docker" "inspect" "112ca2a64762bfdce596e5ee89e1df4cd742a3db7525e79ec22c732b10afab64", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "112ca2a64762bfdce596e5ee89e1df4cd742a3db7525e79ec22c732b10afab64", kill_on_drop: false }`
[INFO] [stdout] 112ca2a64762bfdce596e5ee89e1df4cd742a3db7525e79ec22c732b10afab64
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f547b1fa43abbf0a721c35328d8f54d7d4b2bfad25d7d70cbc56a4d045da0207
[INFO] running `Command { std: "docker" "start" "-a" "f547b1fa43abbf0a721c35328d8f54d7d4b2bfad25d7d70cbc56a4d045da0207", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/yocalhost-c7ff6d7c2cb8def4)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tests::next_port_increments ... ok
[INFO] [stdout] test tests::port_number ... ok
[INFO] [stdout] test tests::starts ... ok
[INFO] [stdout] test tests::high_bandwidth_should_complete_quickly ... FAILED
[INFO] [stdout] test tests::range_request ... ok
[INFO] [stdout] test tests::latency ... FAILED
[INFO] [stdout] test tests::low_bandwidth_should_complete_slowly ... ok
[INFO] [stdout] test tests::concurrent_requests_should_share_bandwidth ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::high_bandwidth_should_complete_quickly stdout ----
[INFO] [stdout] Listening on 127.0.0.1:9903...
[INFO] [stdout] thread 'tests::high_bandwidth_should_complete_quickly' panicked at src/lib.rs:396:9:
[INFO] [stdout] 65.912438ms not within 10ms of 11ms
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a4803ab756 - std::backtrace_rs::backtrace::libunwind::trace::hd7a456af414d63de
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a4803ab756 - std::backtrace_rs::backtrace::trace_unsynchronized::h64867240ea973bd5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a4803ab756 - std::sys_common::backtrace::_print_fmt::h2808b222ea4d26d0
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a4803ab756 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h03f74bc036e21c80
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a4803d7990 - core::fmt::rt::Argument::fmt::h8121cad32ccb67f1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a4803d7990 - core::fmt::write::hba6738a49cae548f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a4803a859f - std::io::Write::write_fmt::h998dc49ddc9bbda8
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a4803ab534 - std::sys_common::backtrace::_print::h12e2732351687df5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a4803ab534 - std::sys_common::backtrace::print::h3977ff4fa70d37c3
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a4803ad2a7 - std::panicking::default_hook::{{closure}}::h3649b42de801f190
[INFO] [stdout]   10:     0x55a4803acf8d - std::panicking::default_hook::h3fb7ccab350417f5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4800b3d97 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcac2ee49c7d5205e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4800b3d97 - test::test_main::{{closure}}::ha6dc19c93a11f2d1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a4803ad8c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h29b8e785b856bb23
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a4803ad8c6 - std::panicking::rust_panic_with_hook::h5efc89ef996de810
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a4803ad612 - std::panicking::begin_panic_handler::{{closure}}::h6289f51ae1ae9efc
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a4803abc56 - std::sys_common::backtrace::__rust_end_short_backtrace::h9f143e0a9d826e65
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a4803ad370 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a47fe943a5 - core::panicking::panic_fmt::h5b9d04f36fd68862
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a47ffd04d1 - yocalhost::tests::high_bandwidth_should_complete_quickly::{{closure}}::hd8eb958eedc21ea1
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:396:9
[INFO] [stdout]   20:     0x55a47ff60188 - <core::pin::Pin<P> as core::future::future::Future>::poll::hbe61b20f40752971
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/future/future.rs:124:9
[INFO] [stdout]   21:     0x55a47ff5fd5b - <core::pin::Pin<P> as core::future::future::Future>::poll::h0da3f3924629659c
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/future/future.rs:124:9
[INFO] [stdout]   22:     0x55a47ffed1b4 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h0bcd60d846d0cf98
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:665:57
[INFO] [stdout]   23:     0x55a47ffed0da - tokio::runtime::coop::with_budget::ha276cc6ca5a99dac
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:107:5
[INFO] [stdout]   24:     0x55a47ffed0da - tokio::runtime::coop::budget::h81561ad81d0cdf10
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:73:5
[INFO] [stdout]   25:     0x55a47ffed0da - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h0563fa41d210f35e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:665:25
[INFO] [stdout]   26:     0x55a47ffebd6c - tokio::runtime::scheduler::current_thread::Context::enter::h832019d3da9dfa92
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:410:19
[INFO] [stdout]   27:     0x55a47ffec8de - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h7758c64669d9e854
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:664:36
[INFO] [stdout]   28:     0x55a47ffec5eb - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hb5a72e8abda53f2e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:743:68
[INFO] [stdout]   29:     0x55a47ff7e6ab - tokio::runtime::context::scoped::Scoped<T>::set::h322531f58ed8db2f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   30:     0x55a47ff43089 - tokio::runtime::context::set_scheduler::{{closure}}::h37fa4e7bd4b7d91d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:26
[INFO] [stdout]   31:     0x55a48004bc86 - std::thread::local::LocalKey<T>::try_with::h21e6a00d516443a5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   32:     0x55a48004b59a - std::thread::local::LocalKey<T>::with::h4d1852a539bd3235
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   33:     0x55a47ff4303d - tokio::runtime::context::set_scheduler::ha4478c4d6face8e9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:9
[INFO] [stdout]   34:     0x55a47ffec380 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::hd0ecfe04bcb9999f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:743:27
[INFO] [stdout]   35:     0x55a47ffec61d - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h675696f1580903ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:652:19
[INFO] [stdout]   36:     0x55a47ffe72ad - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::hc23bba7732bb52e8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:175:28
[INFO] [stdout]   37:     0x55a48004861a - tokio::runtime::context::runtime::enter_runtime::ha720c50710739b9a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   38:     0x55a47ffe71be - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::he19f5e104a0a3463
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:167:9
[INFO] [stdout]   39:     0x55a4800553fd - tokio::runtime::runtime::Runtime::block_on::h14cc15a7278f2ccd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/runtime.rs:348:47
[INFO] [stdout]   40:     0x55a47ffcf8d9 - yocalhost::tests::high_bandwidth_should_complete_quickly::hd8b88d8fcc78a570
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:396:9
[INFO] [stdout]   41:     0x55a47ffcf767 - yocalhost::tests::high_bandwidth_should_complete_quickly::{{closure}}::h99e79c3770a0b8f1
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:385:54
[INFO] [stdout]   42:     0x55a480016ce6 - core::ops::function::FnOnce::call_once::hcb8c77e96f984a92
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x55a4800b959f - core::ops::function::FnOnce::call_once::h547df4cc4781c42c
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x55a4800b959f - test::__rust_begin_short_backtrace::h0751f8da0df8afc9
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:627:18
[INFO] [stdout]   45:     0x55a4800b83f1 - test::run_test_in_process::{{closure}}::h08b7e2b944f5d3bf
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:60
[INFO] [stdout]   46:     0x55a4800b83f1 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4eabe934da23f6d3
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   47:     0x55a4800b83f1 - std::panicking::try::do_call::h8bce2a819a83d75f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40
[INFO] [stdout]   48:     0x55a4800b83f1 - std::panicking::try::h8d0ad43ca1e9dfe4
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19
[INFO] [stdout]   49:     0x55a4800b83f1 - std::panic::catch_unwind::h80c407981483a27f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14
[INFO] [stdout]   50:     0x55a4800b83f1 - test::run_test_in_process::h34f4f1cf26878dcc
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:27
[INFO] [stdout]   51:     0x55a4800b83f1 - test::run_test::{{closure}}::hf98423759bd4e4de
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:573:43
[INFO] [stdout]   52:     0x55a48007f786 - test::run_test::{{closure}}::h31f9214a9865a468
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:601:41
[INFO] [stdout]   53:     0x55a48007f786 - std::sys_common::backtrace::__rust_begin_short_backtrace::h97eebf57e64e4a3e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   54:     0x55a480084887 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h10343cc6e645d5a7
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   55:     0x55a480084887 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h7676f5746d51f304
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   56:     0x55a480084887 - std::panicking::try::do_call::h76c69ddb47b6692d
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40
[INFO] [stdout]   57:     0x55a480084887 - std::panicking::try::h231004126786543e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19
[INFO] [stdout]   58:     0x55a480084887 - std::panic::catch_unwind::h519133dc1360745e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14
[INFO] [stdout]   59:     0x55a480084887 - std::thread::Builder::spawn_unchecked_::{{closure}}::h7c96b1538d88533f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   60:     0x55a480084887 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h90e3a916fbad66da
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   61:     0x55a4803b2585 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h12c26c313019b755
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   62:     0x55a4803b2585 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3a7c22937eaa10d1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   63:     0x55a4803b2585 - std::sys::unix::thread::Thread::new::thread_start::h1ce303acc71f2e7d
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   64:     0x7f7e154ebac3 - <unknown>
[INFO] [stdout]   65:     0x7f7e1557cbf4 - __clone
[INFO] [stdout]   66:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::latency stdout ----
[INFO] [stdout] Listening on 127.0.0.1:9902...
[INFO] [stdout] thread 'tests::latency' panicked at src/lib.rs:370:13:
[INFO] [stdout] 87.961783ms not within 10ms of 50ms
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a4803ab756 - std::backtrace_rs::backtrace::libunwind::trace::hd7a456af414d63de
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a4803ab756 - std::backtrace_rs::backtrace::trace_unsynchronized::h64867240ea973bd5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a4803ab756 - std::sys_common::backtrace::_print_fmt::h2808b222ea4d26d0
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a4803ab756 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h03f74bc036e21c80
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a4803d7990 - core::fmt::rt::Argument::fmt::h8121cad32ccb67f1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a4803d7990 - core::fmt::write::hba6738a49cae548f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a4803a859f - std::io::Write::write_fmt::h998dc49ddc9bbda8
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a4803ab534 - std::sys_common::backtrace::_print::h12e2732351687df5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a4803ab534 - std::sys_common::backtrace::print::h3977ff4fa70d37c3
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a4803ad2a7 - std::panicking::default_hook::{{closure}}::h3649b42de801f190
[INFO] [stdout]   10:     0x55a4803acf8d - std::panicking::default_hook::h3fb7ccab350417f5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4800b3d97 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcac2ee49c7d5205e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4800b3d97 - test::test_main::{{closure}}::ha6dc19c93a11f2d1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a4803ad8c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h29b8e785b856bb23
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a4803ad8c6 - std::panicking::rust_panic_with_hook::h5efc89ef996de810
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a4803ad612 - std::panicking::begin_panic_handler::{{closure}}::h6289f51ae1ae9efc
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a4803abc56 - std::sys_common::backtrace::__rust_end_short_backtrace::h9f143e0a9d826e65
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a4803ad370 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a47fe943a5 - core::panicking::panic_fmt::h5b9d04f36fd68862
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a47ffceee2 - yocalhost::tests::latency::{{closure}}::hc32cc201cf246035
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:370:13
[INFO] [stdout]   20:     0x55a47ff60188 - <core::pin::Pin<P> as core::future::future::Future>::poll::hbe61b20f40752971
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/future/future.rs:124:9
[INFO] [stdout]   21:     0x55a47ff5fd5b - <core::pin::Pin<P> as core::future::future::Future>::poll::h0da3f3924629659c
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/future/future.rs:124:9
[INFO] [stdout]   22:     0x55a47ffed1b4 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h0bcd60d846d0cf98
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:665:57
[INFO] [stdout]   23:     0x55a47ffed0da - tokio::runtime::coop::with_budget::ha276cc6ca5a99dac
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:107:5
[INFO] [stdout]   24:     0x55a47ffed0da - tokio::runtime::coop::budget::h81561ad81d0cdf10
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:73:5
[INFO] [stdout]   25:     0x55a47ffed0da - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h0563fa41d210f35e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:665:25
[INFO] [stdout]   26:     0x55a47ffebd6c - tokio::runtime::scheduler::current_thread::Context::enter::h832019d3da9dfa92
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:410:19
[INFO] [stdout]   27:     0x55a47ffec8de - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h7758c64669d9e854
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:664:36
[INFO] [stdout]   28:     0x55a47ffec5eb - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hb5a72e8abda53f2e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:743:68
[INFO] [stdout]   29:     0x55a47ff7e6ab - tokio::runtime::context::scoped::Scoped<T>::set::h322531f58ed8db2f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   30:     0x55a47ff43089 - tokio::runtime::context::set_scheduler::{{closure}}::h37fa4e7bd4b7d91d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:26
[INFO] [stdout]   31:     0x55a48004bc86 - std::thread::local::LocalKey<T>::try_with::h21e6a00d516443a5
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   32:     0x55a48004b59a - std::thread::local::LocalKey<T>::with::h4d1852a539bd3235
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   33:     0x55a47ff4303d - tokio::runtime::context::set_scheduler::ha4478c4d6face8e9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:9
[INFO] [stdout]   34:     0x55a47ffec380 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::hd0ecfe04bcb9999f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:743:27
[INFO] [stdout]   35:     0x55a47ffec61d - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h675696f1580903ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:652:19
[INFO] [stdout]   36:     0x55a47ffe72ad - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::hc23bba7732bb52e8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:175:28
[INFO] [stdout]   37:     0x55a48004861a - tokio::runtime::context::runtime::enter_runtime::ha720c50710739b9a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   38:     0x55a47ffe71be - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::he19f5e104a0a3463
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/current_thread/mod.rs:167:9
[INFO] [stdout]   39:     0x55a4800553fd - tokio::runtime::runtime::Runtime::block_on::h14cc15a7278f2ccd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/runtime.rs:348:47
[INFO] [stdout]   40:     0x55a47ffce49c - yocalhost::tests::latency::h5d883664b32b255a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:362:9
[INFO] [stdout]   41:     0x55a47ffce327 - yocalhost::tests::latency::{{closure}}::ha0a57f8d05323240
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:361:23
[INFO] [stdout]   42:     0x55a480016ee6 - core::ops::function::FnOnce::call_once::hd38cc2f908d80c68
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x55a4800b959f - core::ops::function::FnOnce::call_once::h547df4cc4781c42c
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x55a4800b959f - test::__rust_begin_short_backtrace::h0751f8da0df8afc9
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:627:18
[INFO] [stdout]   45:     0x55a4800b83f1 - test::run_test_in_process::{{closure}}::h08b7e2b944f5d3bf
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:60
[INFO] [stdout]   46:     0x55a4800b83f1 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4eabe934da23f6d3
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   47:     0x55a4800b83f1 - std::panicking::try::do_call::h8bce2a819a83d75f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40
[INFO] [stdout]   48:     0x55a4800b83f1 - std::panicking::try::h8d0ad43ca1e9dfe4
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19
[INFO] [stdout]   49:     0x55a4800b83f1 - std::panic::catch_unwind::h80c407981483a27f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14
[INFO] [stdout]   50:     0x55a4800b83f1 - test::run_test_in_process::h34f4f1cf26878dcc
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:27
[INFO] [stdout]   51:     0x55a4800b83f1 - test::run_test::{{closure}}::hf98423759bd4e4de
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:573:43
[INFO] [stdout]   52:     0x55a48007f786 - test::run_test::{{closure}}::h31f9214a9865a468
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:601:41
[INFO] [stdout]   53:     0x55a48007f786 - std::sys_common::backtrace::__rust_begin_short_backtrace::h97eebf57e64e4a3e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   54:     0x55a480084887 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h10343cc6e645d5a7
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   55:     0x55a480084887 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h7676f5746d51f304
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   56:     0x55a480084887 - std::panicking::try::do_call::h76c69ddb47b6692d
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40
[INFO] [stdout]   57:     0x55a480084887 - std::panicking::try::h231004126786543e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19
[INFO] [stdout]   58:     0x55a480084887 - std::panic::catch_unwind::h519133dc1360745e
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14
[INFO] [stdout]   59:     0x55a480084887 - std::thread::Builder::spawn_unchecked_::{{closure}}::h7c96b1538d88533f
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   60:     0x55a480084887 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h90e3a916fbad66da
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   61:     0x55a4803b2585 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h12c26c313019b755
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   62:     0x55a4803b2585 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3a7c22937eaa10d1
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   63:     0x55a4803b2585 - std::sys::unix::thread::Thread::new::thread_start::h1ce303acc71f2e7d
[INFO] [stdout]                                at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   64:     0x7f7e154ebac3 - <unknown>
[INFO] [stdout]   65:     0x7f7e1557cbf4 - __clone
[INFO] [stdout]   66:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::high_bandwidth_should_complete_quickly
[INFO] [stdout]     tests::latency
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 6 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.08s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f547b1fa43abbf0a721c35328d8f54d7d4b2bfad25d7d70cbc56a4d045da0207", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f547b1fa43abbf0a721c35328d8f54d7d4b2bfad25d7d70cbc56a4d045da0207", kill_on_drop: false }`
[INFO] [stdout] f547b1fa43abbf0a721c35328d8f54d7d4b2bfad25d7d70cbc56a4d045da0207
